[INFO] fetching crate mace-kv 0.0.28...
[INFO] testing mace-kv-0.0.28 against master#1f7f8ea0721a3b1eb73e6c6d25cccb371434b320 for pr-154065
[INFO] extracting crate mace-kv 0.0.28 into /workspace/builds/worker-6-tc1/source
[INFO] started tweaking crates.io crate mace-kv 0.0.28
[INFO] removed 0 missing examples
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate mace-kv 0.0.28
[INFO] tweaked toml for crates.io crate mace-kv 0.0.28 written to /workspace/builds/worker-6-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate mace-kv 0.0.28 on toolchain 1f7f8ea0721a3b1eb73e6c6d25cccb371434b320
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1f7f8ea0721a3b1eb73e6c6d25cccb371434b320" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate mace-kv 0.0.28 already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1f7f8ea0721a3b1eb73e6c6d25cccb371434b320" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded crc32c v0.6.8
[INFO] [stderr]   Downloaded zerocopy-derive v0.8.41
[INFO] [stderr]   Downloaded btree-store v0.1.4
[INFO] [stderr]   Downloaded zerocopy v0.8.41
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+1f7f8ea0721a3b1eb73e6c6d25cccb371434b320" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 6f8554d1f7dd3e00ffac7a1716765e51acc6c98036c71b91c9b25cf593fb080d
[INFO] running `Command { std: "docker" "start" "-a" "6f8554d1f7dd3e00ffac7a1716765e51acc6c98036c71b91c9b25cf593fb080d", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "6f8554d1f7dd3e00ffac7a1716765e51acc6c98036c71b91c9b25cf593fb080d", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "6f8554d1f7dd3e00ffac7a1716765e51acc6c98036c71b91c9b25cf593fb080d", kill_on_drop: false }`
[INFO] [stdout] 6f8554d1f7dd3e00ffac7a1716765e51acc6c98036c71b91c9b25cf593fb080d
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+1f7f8ea0721a3b1eb73e6c6d25cccb371434b320" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] a7332698d464f7c3cade43fb33440cd0251671e4d962e539ec2d1867fe921be3
[INFO] running `Command { std: "docker" "start" "-a" "a7332698d464f7c3cade43fb33440cd0251671e4d962e539ec2d1867fe921be3", kill_on_drop: false }`
[INFO] [stderr]    Compiling zerocopy v0.8.41
[INFO] [stderr]    Compiling rustc-hash v2.1.1
[INFO] [stderr]    Compiling parking_lot_core v0.9.12
[INFO] [stderr]    Compiling crc32c v0.6.8
[INFO] [stderr]    Compiling crossbeam-epoch v0.9.18
[INFO] [stderr]    Compiling parking_lot v0.12.5
[INFO] [stderr]    Compiling dashmap v6.1.0
[INFO] [stderr]    Compiling btree-store v0.1.4
[INFO] [stderr]    Compiling ppv-lite86 v0.2.21
[INFO] [stderr]    Compiling rand_chacha v0.9.0
[INFO] [stderr]    Compiling rand v0.9.2
[INFO] [stderr]    Compiling mace-kv v0.0.28 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 17.18s
[INFO] running `Command { std: "docker" "inspect" "a7332698d464f7c3cade43fb33440cd0251671e4d962e539ec2d1867fe921be3", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "a7332698d464f7c3cade43fb33440cd0251671e4d962e539ec2d1867fe921be3", kill_on_drop: false }`
[INFO] [stdout] a7332698d464f7c3cade43fb33440cd0251671e4d962e539ec2d1867fe921be3
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+1f7f8ea0721a3b1eb73e6c6d25cccb371434b320" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 7ba911eab41ea805850b1af0aba39c8f64fdf3f4d0d9307efd1065889247372d
[INFO] running `Command { std: "docker" "start" "-a" "7ba911eab41ea805850b1af0aba39c8f64fdf3f4d0d9307efd1065889247372d", kill_on_drop: false }`
[INFO] [stderr]    Compiling zerocopy v0.8.41
[INFO] [stderr]    Compiling cc v1.2.56
[INFO] [stderr]    Compiling rayon-core v1.13.0
[INFO] [stderr]    Compiling regex-syntax v0.8.10
[INFO] [stderr]    Compiling ciborium-io v0.2.2
[INFO] [stderr]    Compiling clap_lex v1.0.0
[INFO] [stderr]    Compiling syn v2.0.117
[INFO] [stderr]    Compiling plotters-backend v0.3.7
[INFO] [stderr]    Compiling itertools v0.13.0
[INFO] [stderr]    Compiling crossbeam-deque v0.8.6
[INFO] [stderr]    Compiling cast v0.3.0
[INFO] [stderr]    Compiling page_size v0.6.0
[INFO] [stderr]    Compiling oorandom v11.1.5
[INFO] [stderr]    Compiling anes v0.1.6
[INFO] [stderr]    Compiling clap_builder v4.5.60
[INFO] [stderr]    Compiling plotters-svg v0.3.7
[INFO] [stderr]    Compiling plotters v0.3.7
[INFO] [stderr]    Compiling rayon v1.11.0
[INFO] [stderr]    Compiling alloca v0.4.0
[INFO] [stderr]    Compiling regex-automata v0.4.14
[INFO] [stderr]    Compiling clap v4.5.60
[INFO] [stderr]    Compiling criterion-plot v0.8.2
[INFO] [stderr]    Compiling zerocopy-derive v0.8.41
[INFO] [stderr]    Compiling serde_derive v1.0.228
[INFO] [stderr]    Compiling regex v1.12.3
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling tinytemplate v1.2.1
[INFO] [stderr]    Compiling ppv-lite86 v0.2.21
[INFO] [stderr]    Compiling half v2.7.1
[INFO] [stderr]    Compiling ciborium-ll v0.2.2
[INFO] [stderr]    Compiling rand_chacha v0.9.0
[INFO] [stderr]    Compiling ciborium v0.2.2
[INFO] [stderr]    Compiling rand v0.9.2
[INFO] [stderr]    Compiling criterion v0.8.2
[INFO] [stderr]    Compiling mace-kv v0.0.28 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 37.96s
[INFO] running `Command { std: "docker" "inspect" "7ba911eab41ea805850b1af0aba39c8f64fdf3f4d0d9307efd1065889247372d", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "7ba911eab41ea805850b1af0aba39c8f64fdf3f4d0d9307efd1065889247372d", kill_on_drop: false }`
[INFO] [stdout] 7ba911eab41ea805850b1af0aba39c8f64fdf3f4d0d9307efd1065889247372d
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+1f7f8ea0721a3b1eb73e6c6d25cccb371434b320" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 1a23747d69b7fba6b381ccf9e5ca622d85ffed352179062c1bd2af79022086b0
[INFO] running `Command { std: "docker" "start" "-a" "1a23747d69b7fba6b381ccf9e5ca622d85ffed352179062c1bd2af79022086b0", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.11s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/mace-3d2708981fc4651c)
[INFO] [stdout] 
[INFO] [stdout] running 56 tests
[INFO] [stdout] test cc::cc::test::commit_tree ... ok
[INFO] [stdout] test cc::context::tests::ccpool_alloc_free_fast_path_keeps_registry_len ... ok
[INFO] [stdout] test cc::context::tests::ccpool_shrink_reclaims_idle_nodes ... ok
[INFO] [stdout] test cc::wal::test::dump_load ... ok
[INFO] [stdout] test cc::wal::test::test_wal_entry_checksums ... ok
[INFO] [stdout] test index::txn::test::prefix_upper_exclusive_handles_carry ... ok
[INFO] [stdout] test map::flow::test::flush_pacing_bypasses_on_teardown_flag ... ok
[INFO] [stdout] test map::flow::test::debt_reconciles_when_actual_below_estimate ... ok
[INFO] [stdout] test map::flow::test::arena_starving_scope_is_reference_counted ... ok
[INFO] [stdout] test map::flow::test::flush_pacing_bypasses_under_high_debt ... ok
[INFO] [stdout] test map::flow::test::flush_pacing_uses_dedicated_threshold_instead_of_foreground_soft_limit ... ok
[INFO] [stdout] test map::flow::test::foreground_backpressure_skips_cold_start_before_fail_safe_backlog ... ok
[INFO] [stdout] test meta::entry::test::pending_retire_codec_roundtrip ... ok
[INFO] [stdout] test map::flow::test::debt_reconciles_when_actual_exceeds_estimate ... ok
[INFO] [stdout] test meta::entry::test::pending_sibling_codec_roundtrip ... ok
[INFO] [stdout] test map::flow::test::teardown_scope_bypasses_pacing_for_normal_tasks ... ok
[INFO] [stdout] test types::base::test::box_base ... ok
[INFO] [stdout] test map::flow::test::metadata_only_mark_done_settles_once_without_ewma_sample ... ok
[INFO] [stdout] test types::base::test::builder_intl ... ok
[INFO] [stdout] test types::base::test::builder_leaf ... ok
[INFO] [stdout] test types::base::test::merge_leaf_with_different_prefix_lengths_keeps_distinct_raw_keys ... ok
[INFO] [stdout] test types::data::test::full_raw_cmp_handles_one_side_empty_prefix ... ok
[INFO] [stdout] test types::data::test::leaf_seg_full_raw_cmp_handles_prefix_boundary ... ok
[INFO] [stdout] test types::data::test::test_index_codec ... ok
[INFO] [stdout] test types::data::test::test_key_codec ... ok
[INFO] [stdout] test types::data::test::test_ver ... ok
[INFO] [stdout] test types::data::test::test_val_codec ... ok
[INFO] [stdout] test types::node::test::garbage_collect_collects_whole_sibling_chain ... ok
[INFO] [stdout] test types::node::test::merge_overlay_keeps_delta_changes ... ok
[INFO] [stdout] test utils::bitmap::test::bitmap ... ok
[INFO] [stdout] test types::node::test::split_overlay_keeps_delta_changes ... ok
[INFO] [stdout] test types::node::test::leaf_iter ... ok
[INFO] [stdout] test utils::imtree::test::leak ... ok
[INFO] [stdout] test utils::interval::test::basic_operations ... ok
[INFO] [stdout] test utils::imtree::test::simple ... ok
[INFO] [stdout] test map::table::test::publish_reserved_makes_pid_visible_once ... ok
[INFO] [stdout] test utils::lru::test::lru ... ok
[INFO] [stdout] test utils::observe::test::snapshot_counts ... ok
[INFO] [stdout] test map::table::test::reserve_pid_drop_returns_pid_to_free ... ok
[INFO] [stdout] test utils::test::test_free_functions ... ok
[INFO] [stdout] test utils::varint::test::test_varint32 ... ok
[INFO] [stdout] test utils::varint::test::test_varint64 ... ok
[INFO] [stdout] test map::flow::test::idle_reset_clears_stale_samples ... ok
[INFO] [stdout] test map::flow::test::flush_pacing_sleeps_under_low_debt ... ok
[INFO] [stdout] test map::table::test::test_page_map ... ok
[INFO] [stdout] test map::flow::test::foreground_backpressure_sleeps_when_steady_state_debt_exceeds_stop ... ok
[INFO] [stdout] test utils::queue::test::test_queue ... ok
[INFO] [stdout] test utils::interval::test::moha - should panic ... ok
[INFO] [stdout] test map::data::test::data_dump_load ... ok
[INFO] [stdout] test utils::interval::test::merge_split ... ok
[INFO] [stdout] test utils::queue::test::test_queue2 ... ok
[INFO] [stdout] test index::txn::test::cross_long_txn ... ok
[INFO] [stdout] test index::txn::test::txnkv ... ok
[INFO] [stdout] test index::tree::test::concurrent_page_hit ... ok
[INFO] [stdout] test index::tree::test::concurrent_page_hit_runtime_smo has been running for over 60 seconds
[INFO] [stdout] test index::tree::test::runtime_smo_merge_retry_idempotence_stress has been running for over 60 seconds
[INFO] [stdout] test index::tree::test::concurrent_page_hit_runtime_smo ... ok
[INFO] [stdout] test index::tree::test::runtime_smo_merge_retry_idempotence_stress ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 56 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 73.81s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/anomalies.rs (/opt/rustwide/target/debug/deps/anomalies-634fb9288c33b0f1)
[INFO] [stdout] 
[INFO] [stdout] running 12 tests
[INFO] [stdout] test no_g1_b ... ok
[INFO] [stdout] test no_p0_2 ... ok
[INFO] [stdout] test no_g0 ... ok
[INFO] [stdout] test no_g1_c ... ok
[INFO] [stdout] test history ... ok
[INFO] [stdout] test no_g1_a ... ok
[INFO] [stdout] test no_g2 ... ok
[INFO] [stdout] test no_p0_1 ... ok
[INFO] [stdout] test no_otv ... ok
[INFO] [stdout] test write_skew - should panic ... ok
[INFO] [stdout] test no_p4 ... ok
[INFO] [stderr]      Running tests/backpressure.rs (/opt/rustwide/target/debug/deps/backpressure-2e371c5a057266e3)
[INFO] [stdout] test no_pmp ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 12 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.91s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 5 tests
[INFO] [stdout] test teardown_and_starvation_bypass_hold_under_multi_bucket_concurrency ... ok
[INFO] [stdout] test arena_spill_exhaustion_keeps_progress_with_internal_retry ... ok
[INFO] [stdout] test write_backpressure_emits_observe_metrics ... ok
[INFO] [stdout] test flush_pacing_emits_bypass_metrics_under_high_pressure ... ok
[INFO] [stdout] test flush_pacing_avoids_high_debt_bypass_under_low_debt ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 8.35s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/bench.rs (/opt/rustwide/target/debug/deps/bench-dd9b76c65ed69ce9)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test bench ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 9.98s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/big.rs (/opt/rustwide/target/debug/deps/big-2fbc199cc771c95f)
[INFO] [stdout] 
[INFO] [stdout] running 4 tests
[INFO] [stdout] test big_kv2 ... ok
[INFO] [stdout] test big_kv ... ok
[INFO] [stdout] test big_kv3 ... ok
[INFO] [stdout] test upsert_delete ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 28.93s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/bucket.rs (/opt/rustwide/target/debug/deps/bucket-0aeb5501dbad8d20)
[INFO] [stdout] 
[INFO] [stdout] running 13 tests
[INFO] [stderr] error: test failed, to rerun pass `--test bucket`
[INFO] [stderr] 
[INFO] [stderr] Caused by:
[INFO] [stderr]   process didn't exit successfully: `/opt/rustwide/target/debug/deps/bucket-0aeb5501dbad8d20` (signal: 9, SIGKILL: kill)
[INFO] running `Command { std: "docker" "inspect" "1a23747d69b7fba6b381ccf9e5ca622d85ffed352179062c1bd2af79022086b0", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "1a23747d69b7fba6b381ccf9e5ca622d85ffed352179062c1bd2af79022086b0", kill_on_drop: false }`
[INFO] [stdout] 1a23747d69b7fba6b381ccf9e5ca622d85ffed352179062c1bd2af79022086b0
